[INFO] fetching crate mls-rs-provider-sqlite 0.22.0...
[INFO] testing mls-rs-provider-sqlite-0.22.0 against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065-1
[INFO] extracting crate mls-rs-provider-sqlite 0.22.0 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate mls-rs-provider-sqlite 0.22.0
[INFO] finished tweaking crates.io crate mls-rs-provider-sqlite 0.22.0
[INFO] tweaked toml for crates.io crate mls-rs-provider-sqlite 0.22.0 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate mls-rs-provider-sqlite 0.22.0 on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate mls-rs-provider-sqlite 0.22.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 7a444aabde5eaa5d3e7a0b76aef4ecbab7b00bb35b9d5c8f35b0e0e666aa0863
[INFO] running `Command { std: "docker" "start" "-a" "7a444aabde5eaa5d3e7a0b76aef4ecbab7b00bb35b9d5c8f35b0e0e666aa0863", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7a444aabde5eaa5d3e7a0b76aef4ecbab7b00bb35b9d5c8f35b0e0e666aa0863", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7a444aabde5eaa5d3e7a0b76aef4ecbab7b00bb35b9d5c8f35b0e0e666aa0863", kill_on_drop: false }`
[INFO] [stdout] 7a444aabde5eaa5d3e7a0b76aef4ecbab7b00bb35b9d5c8f35b0e0e666aa0863
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c493bdd94c9607987f38641cc5c7cd717c3d0d0b6c3148b65360894c54c30c3d
[INFO] running `Command { std: "docker" "start" "-a" "c493bdd94c9607987f38641cc5c7cd717c3d0d0b6c3148b65360894c54c30c3d", kill_on_drop: false }`
[INFO] [stderr]    Compiling cc v1.2.57
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling hashlink v0.10.0
[INFO] [stderr]    Compiling libsqlite3-sys v0.35.0
[INFO] [stderr]    Compiling darling_core v0.20.11
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling zeroize_derive v1.4.3
[INFO] [stderr]    Compiling maybe-async v0.2.10
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling darling_macro v0.20.11
[INFO] [stderr]    Compiling darling v0.20.11
[INFO] [stderr]    Compiling mls-rs-codec-derive v0.2.0
[INFO] [stderr]    Compiling mls-rs-codec v0.7.0
[INFO] [stderr]    Compiling mls-rs-core v0.26.0
[INFO] [stderr]    Compiling rusqlite v0.37.0
[INFO] [stderr]    Compiling mls-rs-provider-sqlite v0.22.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 30.82s
[INFO] running `Command { std: "docker" "inspect" "c493bdd94c9607987f38641cc5c7cd717c3d0d0b6c3148b65360894c54c30c3d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c493bdd94c9607987f38641cc5c7cd717c3d0d0b6c3148b65360894c54c30c3d", kill_on_drop: false }`
[INFO] [stdout] c493bdd94c9607987f38641cc5c7cd717c3d0d0b6c3148b65360894c54c30c3d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] be61924947629259b73c981868ca765c663c8f38ff30edbbf343a94cd8df8207
[INFO] running `Command { std: "docker" "start" "-a" "be61924947629259b73c981868ca765c663c8f38ff30edbbf343a94cd8df8207", kill_on_drop: false }`
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling zerocopy v0.8.47
[INFO] [stderr]    Compiling rusqlite v0.37.0
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling assert_matches v1.5.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling mls-rs-provider-sqlite v0.22.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 10.26s
[INFO] running `Command { std: "docker" "inspect" "be61924947629259b73c981868ca765c663c8f38ff30edbbf343a94cd8df8207", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "be61924947629259b73c981868ca765c663c8f38ff30edbbf343a94cd8df8207", kill_on_drop: false }`
[INFO] [stdout] be61924947629259b73c981868ca765c663c8f38ff30edbbf343a94cd8df8207
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 43ce3dfdcf155acdfc13083db9bbc97c997efdfa0b81cae594e19d0510e7cb21
[INFO] running `Command { std: "docker" "start" "-a" "43ce3dfdcf155acdfc13083db9bbc97c997efdfa0b81cae594e19d0510e7cb21", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mls_rs_provider_sqlite-d9e65600a60b308c)
[INFO] [stdout] 
[INFO] [stdout] running 36 tests
[INFO] [stdout] test cipher::tests::sql_cipher_invalid_key_plaintext_header ... ok
[INFO] [stdout] test application::tests::batch_insert ... ok
[INFO] [stdout] test application::tests::test_by_prefix ... ok
[INFO] [stdout] test application::tests::test_special_characters ... ok
[INFO] [stdout] test application::tests::test_insert_existing_overwrite ... ok
[INFO] [stdout] test application::tests::test_insert ... ok
[INFO] [stdout] test group_state::tests::epoch_id_overflow ... ok
[INFO] [stdout] test application::tests::test_delete ... ok
[INFO] [stdout] test application::tests::test_duplicate_insert ... ok
[INFO] [stdout] test group_state::tests::delete_group ... ok
[INFO] [stdout] test group_state::tests::group_can_be_initially_stored ... ok
[INFO] [stdout] test group_state::tests::max_epoch_is_none_for_non_persisted_group ... ok
[INFO] [stdout] test group_state::tests::epoch_insert_update_old_epoch ... ok
[INFO] [stdout] test group_state::tests::max_epoch_is_none_when_no_epochs ... ok
[INFO] [stdout] test group_state::tests::max_epoch_can_be_calculated ... ok
[INFO] [stdout] test group_state::tests::epochs_are_truncated ... ok
[INFO] [stdout] test key_package::tests::expired_key_package_gelete ... ok
[INFO] [stdout] test group_state::tests::muiltiple_groups_can_exist ... ok
[INFO] [stdout] test cipher::tests::sql_cipher_raw_key ... ok
[INFO] [stderr] 2026-03-30 04:20:54.926: ERROR CORE sqlcipher_page_cipher: hmac check failed for pgno=1
[INFO] [stdout] test cipher::tests::sql_cipher_raw_key_salt ... ok
[INFO] [stderr] 2026-03-30 04:20:54.929: ERROR CORE sqlite3Codec: error decrypting page 1 data: 1
[INFO] [stdout] test key_package::tests::key_package_insert ... ok
[INFO] [stderr] 2026-03-30 04:20:54.929: ERROR CORE sqlcipher_codec_ctx_set_error 1
[INFO] [stdout] test cipher::tests::sql_cipher_plaintext_header ... ok
[INFO] [stderr] 2026-03-30 04:20:54.929: ERROR CORE sqlcipher_page_cipher: hmac check failed for pgno=1
[INFO] [stdout] test key_package::tests::key_package_delete ... ok
[INFO] [stderr] 2026-03-30 04:20:54.930: ERROR CORE sqlite3Codec: error decrypting page 1 data: 1
[INFO] [stdout] test group_state::tests::snapshot_and_epoch_can_be_updated ... ok
[INFO] [stderr] 2026-03-30 04:20:54.930: ERROR CORE sqlcipher_codec_ctx_set_error 1
[INFO] [stdout] test key_package::tests::duplicate_insert_should_fail ... ok
[INFO] [stderr] 2026-03-30 04:20:54.929: ERROR CORE sqlcipher_page_cipher: hmac check failed for pgno=1
[INFO] [stdout] test key_package::tests::key_count_at_time ... ok
[INFO] [stderr] 2026-03-30 04:20:54.930: ERROR CORE sqlite3Codec: error decrypting page 1 data: 1
[INFO] [stderr] 2026-03-30 04:20:54.930: ERROR CORE sqlcipher_codec_ctx_set_error 1
[INFO] [stdout] test key_package::tests::key_count ... ok
[INFO] [stdout] test psk::tests::test_delete ... ok
[INFO] [stdout] test key_package::tests::timestamp_overflow ... ok
[INFO] [stdout] test key_package::tests::key_package_not_found ... ok
[INFO] [stdout] test psk::tests::test_insert ... ok
[INFO] [stdout] test psk::tests::test_insert_existing_overwrite ... ok
[INFO] [stdout] test tests::user_version_test ... ok
[INFO] [stdout] test tests::extended_schema_version_test ... ok
[INFO] [stdout] test tests::journal_mode_test ... ok
[INFO] [stdout] test cipher::tests::sql_cipher_passphrase ... ok
[INFO] [stderr] 2026-03-30 04:20:56.146: ERROR CORE sqlcipher_page_cipher: hmac check failed for pgno=1
[INFO] [stdout] 
[INFO] [stderr] 2026-03-30 04:20:56.146: ERROR CORE sqlite3Codec: error decrypting page 1 data: 1
[INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.26s
[INFO] [stderr] 2026-03-30 04:20:56.146: ERROR CORE sqlcipher_codec_ctx_set_error 1
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests mls_rs_provider_sqlite
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "43ce3dfdcf155acdfc13083db9bbc97c997efdfa0b81cae594e19d0510e7cb21", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "43ce3dfdcf155acdfc13083db9bbc97c997efdfa0b81cae594e19d0510e7cb21", kill_on_drop: false }`
[INFO] [stdout] 43ce3dfdcf155acdfc13083db9bbc97c997efdfa0b81cae594e19d0510e7cb21
